[INFO] fetching crate saku-storage 0.4.0...
[INFO] testing saku-storage-0.4.0 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate saku-storage 0.4.0 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate saku-storage 0.4.0
[INFO] finished tweaking crates.io crate saku-storage 0.4.0
[INFO] tweaked toml for crates.io crate saku-storage 0.4.0 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate saku-storage 0.4.0 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate saku-storage 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 10d2942ada1b03c5f7bdf048c89bf5fd652fca425ceed37da6c46769f7d035fb
[INFO] running `Command { std: "docker" "start" "-a" "10d2942ada1b03c5f7bdf048c89bf5fd652fca425ceed37da6c46769f7d035fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "10d2942ada1b03c5f7bdf048c89bf5fd652fca425ceed37da6c46769f7d035fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10d2942ada1b03c5f7bdf048c89bf5fd652fca425ceed37da6c46769f7d035fb", kill_on_drop: false }`
[INFO] [stdout] 10d2942ada1b03c5f7bdf048c89bf5fd652fca425ceed37da6c46769f7d035fb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a200709831563680bccf9b8b16f875e26a78c84ec96946ce8646823228064397
[INFO] running `Command { std: "docker" "start" "-a" "a200709831563680bccf9b8b16f875e26a78c84ec96946ce8646823228064397", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling libc v0.2.181
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling syn v2.0.115
[INFO] [stderr]    Compiling cpufeatures v0.2.17
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling fs2 v0.4.3
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling jiff v0.2.20
[INFO] [stderr]    Compiling uuid v1.20.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling saku-storage v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.77s
[INFO] running `Command { std: "docker" "inspect" "a200709831563680bccf9b8b16f875e26a78c84ec96946ce8646823228064397", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a200709831563680bccf9b8b16f875e26a78c84ec96946ce8646823228064397", kill_on_drop: false }`
[INFO] [stdout] a200709831563680bccf9b8b16f875e26a78c84ec96946ce8646823228064397
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bbbfb86f5ae0722064db5351466ce688fc4de0274d11aba3d2ed36f3dfd768a3
[INFO] running `Command { std: "docker" "start" "-a" "bbbfb86f5ae0722064db5351466ce688fc4de0274d11aba3d2ed36f3dfd768a3", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling saku-storage v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.23s
[INFO] running `Command { std: "docker" "inspect" "bbbfb86f5ae0722064db5351466ce688fc4de0274d11aba3d2ed36f3dfd768a3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bbbfb86f5ae0722064db5351466ce688fc4de0274d11aba3d2ed36f3dfd768a3", kill_on_drop: false }`
[INFO] [stdout] bbbfb86f5ae0722064db5351466ce688fc4de0274d11aba3d2ed36f3dfd768a3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 60d35559f6ad5784124e43a302bd2294acb27f58d7da228a0dea546a941da599
[INFO] running `Command { std: "docker" "start" "-a" "60d35559f6ad5784124e43a302bd2294acb27f58d7da228a0dea546a941da599", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/saku_storage-845c0e58853b5564)
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test dirty_tracker::tests::clear_all_empties_set ... ok
[INFO] [stdout] test device::tests::saku_data_dir_returns_path ... ok
[INFO] [stdout] test dirty_tracker::tests::clear_dirty_removes_keys ... ok
[INFO] [stdout] test dirty_tracker::tests::mark_dirty_adds_key ... ok
[INFO] [stdout] test dirty_tracker::tests::mark_dirty_is_idempotent ... ok
[INFO] [stdout] test dirty_tracker::tests::mark_dirty_many ... ok
[INFO] [stdout] test dirty_tracker::tests::load_corrupt_file_returns_empty ... ok
[INFO] [stdout] test dirty_tracker::tests::load_missing_file_returns_empty ... ok
[INFO] [stdout] test dirty_tracker::tests::save_and_load_roundtrip ... ok
[INFO] [stdout] test dirty_tracker::tests::new_tracker_is_empty ... ok
[INFO] [stdout] test dirty_tracker::tests::sidecar_path_from_store_path ... ok
[INFO] [stdout] test dirty_tracker::tests::set_cookie_updates_value ... ok
[INFO] [stdout] test entity::tests::natural_key_is_lowercase ... ok
[INFO] [stdout] test device::tests::creates_device_id_on_first_run ... ok
[INFO] [stdout] test entity::tests::storage_key_combines_type_and_natural_key ... ok
[INFO] [stdout] test io::backup::tests::backup_dir_is_sibling ... ok
[INFO] [stdout] test io::atomic_writer::tests::writes_content_atomically ... ok
[INFO] [stdout] test key_gen::tests::base36_encode_large_value ... ok
[INFO] [stdout] test key_gen::tests::base36_encode_small_values ... ok
[INFO] [stdout] test key_gen::tests::base36_encode_zero ... ok
[INFO] [stdout] test key_gen::tests::generate_task_key_different_devices_produce_different_keys ... ok
[INFO] [stdout] test io::backup::tests::no_backup_when_source_missing ... ok
[INFO] [stdout] test key_gen::tests::generate_task_key_different_timestamps_produce_different_keys ... ok
[INFO] [stdout] test io::file_lock::tests::acquire_and_release ... ok
[INFO] [stdout] test io::atomic_writer::tests::overwrites_existing_file ... ok
[INFO] [stdout] test key_gen::tests::generate_task_key_is_deterministic ... ok
[INFO] [stdout] test key_gen::tests::generate_task_key_is_not_empty ... ok
[INFO] [stdout] test kv_store::tests::compare_modified_at_equal_timestamps ... ok
[INFO] [stdout] test kv_store::tests::compare_modified_at_higher_wall_ms_wins ... ok
[INFO] [stdout] test kv_store::tests::compare_modified_at_missing_field_returns_equal ... ok
[INFO] [stdout] test kv_store::tests::gc_tombstones_keeps_all_when_young ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_live_wins_over_tombstone_when_newer ... ok
[INFO] [stdout] test kv_store::tests::gc_tombstones_removes_old_tombstones ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_new_keys_from_both_sides ... ok
[INFO] [stdout] test device::tests::returns_same_id_on_subsequent_reads ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_picks_higher_version ... ok
[INFO] [stdout] test kv_store::tests::reconcile_renames_single_rename_is_noop ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_same_key_higher_wins ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_same_key_local_wins_when_newer ... ok
[INFO] [stdout] test kv_store::tests::lww_merge_kv_tombstone_wins_over_live_when_newer ... ok
[INFO] [stdout] test kv_store::tests::reconcile_renames_chain_gets_shortcut ... ok
[INFO] [stdout] test kv_store::tests::repair_references_fixes_array_refs ... ok
[INFO] [stdout] test kv_store::tests::repair_references_follows_chain ... ok
[INFO] [stdout] test timestamp::tests::default_is_zero ... ok
[INFO] [stdout] test kv_store::tests::repair_references_fixes_dangling_single_ref ... ok
[INFO] [stdout] test timestamp::tests::equality ... ok
[INFO] [stdout] test timestamp::tests::ordering_lamport_breaks_wall_ms_tie ... ok
[INFO] [stdout] test timestamp::tests::from_jiff_produces_correct_wall_ms ... ok
[INFO] [stdout] test timestamp::tests::ordering_device_id_breaks_lamport_tie ... ok
[INFO] [stdout] test timestamp::tests::ordering_wall_ms_takes_priority ... ok
[INFO] [stdout] test timestamp::tests::serde_roundtrip ... ok
[INFO] [stdout] test kv_store::tests::repair_references_no_renames_is_noop ... ok
[INFO] [stdout] test io::backup::tests::creates_backup_and_cleans_up ... ok
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests saku_storage
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "60d35559f6ad5784124e43a302bd2294acb27f58d7da228a0dea546a941da599", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "60d35559f6ad5784124e43a302bd2294acb27f58d7da228a0dea546a941da599", kill_on_drop: false }`
[INFO] [stdout] 60d35559f6ad5784124e43a302bd2294acb27f58d7da228a0dea546a941da599
